[INFO] fetching crate pbench 0.2.0...
[INFO] testing pbench-0.2.0 against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065-1
[INFO] extracting crate pbench 0.2.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate pbench 0.2.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate pbench 0.2.0
[INFO] tweaked toml for crates.io crate pbench 0.2.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate pbench 0.2.0 on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate pbench 0.2.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded pbench-macros v0.2.0
[INFO] [stderr]   Downloaded target-triple v1.0.0
[INFO] [stderr]   Downloaded saa v5.5.0
[INFO] [stderr]   Downloaded trybuild v1.0.116
[INFO] [stderr]   Downloaded mimalloc v0.1.48
[INFO] [stderr]   Downloaded sdd v4.6.2
[INFO] [stderr]   Downloaded seize v0.5.1
[INFO] [stderr]   Downloaded toml v1.0.2+spec-1.1.0
[INFO] [stderr]   Downloaded scc v3.6.5
[INFO] [stderr]   Downloaded masstree v0.8.1
[INFO] [stderr]   Downloaded libmimalloc-sys v0.1.44
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5a61a5abf62411dcfeff1b4371699c1f995362cdf1d27d4781da1f44fda81b7c
[INFO] running `Command { std: "docker" "start" "-a" "5a61a5abf62411dcfeff1b4371699c1f995362cdf1d27d4781da1f44fda81b7c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5a61a5abf62411dcfeff1b4371699c1f995362cdf1d27d4781da1f44fda81b7c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5a61a5abf62411dcfeff1b4371699c1f995362cdf1d27d4781da1f44fda81b7c", kill_on_drop: false }`
[INFO] [stdout] 5a61a5abf62411dcfeff1b4371699c1f995362cdf1d27d4781da1f44fda81b7c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] db747dbc1834d8015108b4de6b2506f86a3951c75a2c365bb00556b2a9192ddd
[INFO] running `Command { std: "docker" "start" "-a" "db747dbc1834d8015108b4de6b2506f86a3951c75a2c365bb00556b2a9192ddd", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling base64 v0.21.7
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling hdrhistogram v7.5.4
[INFO] [stderr]    Compiling pbench-macros v0.2.0
[INFO] [stderr]    Compiling pbench v0.2.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unnecessary `unsafe` block
[INFO] [stdout]   --> src/time/tsc.rs:97:9
[INFO] [stdout]    |
[INFO] [stdout] 97 |         unsafe { x86::__cpuid(leaf) }
[INFO] [stdout]    |         ^^^^^^ unnecessary `unsafe` block
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.32s
[INFO] running `Command { std: "docker" "inspect" "db747dbc1834d8015108b4de6b2506f86a3951c75a2c365bb00556b2a9192ddd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "db747dbc1834d8015108b4de6b2506f86a3951c75a2c365bb00556b2a9192ddd", kill_on_drop: false }`
[INFO] [stdout] db747dbc1834d8015108b4de6b2506f86a3951c75a2c365bb00556b2a9192ddd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 20f5e2b22ab0d95a11be97797a4ea9f6648323a5cee30c11554a33a6e20e9b51
[INFO] running `Command { std: "docker" "start" "-a" "20f5e2b22ab0d95a11be97797a4ea9f6648323a5cee30c11554a33a6e20e9b51", kill_on_drop: false }`
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling target-triple v1.0.0
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling toml_datetime v1.0.0+spec-1.1.0
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling seize v0.5.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling sdd v4.6.2
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling rustc-hash v2.1.1
[INFO] [stderr]    Compiling saa v5.5.0
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling dashmap v6.1.0
[INFO] [stderr]    Compiling scc v3.6.5
[INFO] [stderr]    Compiling hdrhistogram v7.5.4
[INFO] [stderr]    Compiling libmimalloc-sys v0.1.44
[INFO] [stderr]    Compiling pbench v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling toml_parser v1.0.9+spec-1.1.0
[INFO] [stderr]    Compiling toml v1.0.2+spec-1.1.0
[INFO] [stdout] warning: unnecessary `unsafe` block
[INFO] [stdout]   --> src/time/tsc.rs:97:9
[INFO] [stdout]    |
[INFO] [stdout] 97 |         unsafe { x86::__cpuid(leaf) }
[INFO] [stdout]    |         ^^^^^^ unnecessary `unsafe` block
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling mimalloc v0.1.48
[INFO] [stderr]    Compiling masstree v0.8.1
[INFO] [stderr]    Compiling trybuild v1.0.116
[INFO] [stdout] warning: unnecessary `unsafe` block
[INFO] [stdout]   --> src/time/tsc.rs:97:9
[INFO] [stdout]    |
[INFO] [stdout] 97 |         unsafe { x86::__cpuid(leaf) }
[INFO] [stdout]    |         ^^^^^^ unnecessary `unsafe` block
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 15.37s
[INFO] running `Command { std: "docker" "inspect" "20f5e2b22ab0d95a11be97797a4ea9f6648323a5cee30c11554a33a6e20e9b51", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "20f5e2b22ab0d95a11be97797a4ea9f6648323a5cee30c11554a33a6e20e9b51", kill_on_drop: false }`
[INFO] [stdout] 20f5e2b22ab0d95a11be97797a4ea9f6648323a5cee30c11554a33a6e20e9b51
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d8963d2d6ad7d3d71eec193422852bfa7498fe074e2ea1b4a91eeed797cc6371
[INFO] running `Command { std: "docker" "start" "-a" "d8963d2d6ad7d3d71eec193422852bfa7498fe074e2ea1b4a91eeed797cc6371", kill_on_drop: false }`
[INFO] [stderr] warning: unnecessary `unsafe` block
[INFO] [stderr]   --> src/time/tsc.rs:97:9
[INFO] [stderr]    |
[INFO] [stderr] 97 |         unsafe { x86::__cpuid(leaf) }
[INFO] [stderr]    |         ^^^^^^ unnecessary `unsafe` block
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `pbench` (lib) generated 1 warning
[INFO] [stderr] warning: `pbench` (lib test) generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/pbench-ae853d4588caf6ef)
[INFO] [stdout] 
[INFO] [stdout] running 241 tests
[INFO] [stdout] test bencher::unit_tests::bench_context_zero_threads_panics - should panic ... ok
[INFO] [stdout] test bencher::unit_tests::bench_values_string_output ... ok
[INFO] [stdout] test bencher::unit_tests::bench_values_collects_samples ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_threaded_propagates_panic - should panic ... ok
[INFO] [stdout] test bencher::unit_tests::bench_with_counter ... ok
[INFO] [stdout] test bencher::unit_tests::context_finish_without_run_returns_none ... ok
[INFO] [stdout] test bencher::unit_tests::adaptive_tuning_produces_stats ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_threaded_sample_count_is_total_not_per_thread ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_unit_output ... ok
[INFO] [stdout] test bencher::unit_tests::bench_values_drop_correctness ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_threaded_four_threads ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_threaded_with_one_thread_matches_single ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_threaded_counter_length_matches_sample_count ... ok
[INFO] [stdout] test bencher::unit_tests::bench_without_counter_has_no_collection ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_i32_output ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_collects_samples ... ok
[INFO] [stdout] test bencher::unit_tests::bench_values_threaded_collects_samples ... ok
[INFO] [stdout] test bencher::unit_tests::bench_refs_threaded_collects_samples ... ok
[INFO] [stdout] test bencher::unit_tests::counter_with_adaptive_tuning ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_values_threaded_drop_correctness ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_values_threaded ... ok
[INFO] [stdout] test cli::unit_tests::parse_bytes_format ... ok
[INFO] [stdout] test bencher::unit_tests::counter_overwrite_uses_last_value ... ok
[INFO] [stdout] test cli::unit_tests::parse_filter ... ok
[INFO] [stdout] test cli::unit_tests::parse_ignored ... ok
[INFO] [stdout] test cli::unit_tests::parse_include_ignored ... ok
[INFO] [stdout] test cli::unit_tests::parse_invalid_output ... ok
[INFO] [stdout] test cli::unit_tests::parse_invalid_sort ... ok
[INFO] [stdout] test cli::unit_tests::parse_invalid_threshold ... ok
[INFO] [stdout] test cli::unit_tests::parse_list ... ok
[INFO] [stdout] test cli::unit_tests::parse_list_terse ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_refs_threaded_counter_matches ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_default_none ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_invalid_unit ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_microseconds ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_milliseconds ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_missing_unit ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_nanoseconds ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_no_number ... ok
[INFO] [stdout] test cli::unit_tests::parse_min_time_seconds ... ok
[INFO] [stdout] test cli::unit_tests::parse_output_json ... ok
[INFO] [stdout] test cli::unit_tests::parse_save_baseline ... ok
[INFO] [stdout] test cli::unit_tests::parse_skip ... ok
[INFO] [stdout] test cli::unit_tests::parse_skip_overrides_filter ... ok
[INFO] [stdout] test cli::unit_tests::parse_sort ... ok
[INFO] [stdout] test cli::unit_tests::parse_test ... ok
[INFO] [stdout] test cli::unit_tests::parse_threads_multiple ... ok
[INFO] [stdout] test cli::unit_tests::parse_threads_no_flag ... ok
[INFO] [stdout] test cli::unit_tests::parse_threads_single ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_calls_generator_per_iteration ... ok
[INFO] [stdout] test cli::unit_tests::parse_threads_zero ... ok
[INFO] [stdout] test cli::unit_tests::parse_threads_zero_mixed ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_values_threaded_non_divisible_sample_count ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_refs ... ok
[INFO] [stdout] test cli::unit_tests::parse_unknown_flag ... ok
[INFO] [stdout] test config::unit_tests::defaults_all_none ... ok
[INFO] [stdout] test config::unit_tests::overwrite_all_fields_child_wins ... ok
[INFO] [stdout] test config::unit_tests::overwrite_inheritance ... ok
[INFO] [stdout] test config::unit_tests::overwrite_precedence ... ok
[INFO] [stdout] test config::unit_tests::overwrite_threads_inherits_from_parent ... ok
[INFO] [stdout] test config::unit_tests::resolve_defaults ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_provides_fresh_input ... ok
[INFO] [stdout] test config::unit_tests::resolve_threads_default_is_single ... ok
[INFO] [stdout] test config::unit_tests::resolve_partial ... ok
[INFO] [stdout] test config::unit_tests::resolve_threads_explicit_list ... ok
[INFO] [stdout] test config::unit_tests::resolve_threads_zero_expands_to_available ... ok
[INFO] [stdout] test config::unit_tests::resolve_threads_sorted_and_deduped ... ok
[INFO] [stdout] test config::unit_tests::resolve_threads_zero_mixed_with_explicit ... ok
[INFO] [stdout] test bencher::unit_tests::counter_with_multi_iteration_samples ... ok
[INFO] [stdout] test counter::collection::unit_tests::mean_count_empty ... ok
[INFO] [stdout] test counter::collection::unit_tests::counts_returns_raw_values ... ok
[INFO] [stdout] test counter::collection::unit_tests::mean_count_large_values_no_overflow ... ok
[INFO] [stdout] test counter::collection::unit_tests::mean_count_single ... ok
[INFO] [stdout] test counter::collection::unit_tests::mean_count_non_integer ... ok
[INFO] [stdout] test bencher::unit_tests::second_run_panics - should panic ... ok
[INFO] [stdout] test bencher::unit_tests::bench_with_counter_via_context_finish ... ok
[INFO] [stdout] test cli::unit_tests::parse_threshold ... ok
[INFO] [stdout] test counter::collection::unit_tests::mean_count_multiple ... ok
[INFO] [stdout] test counter::collection::unit_tests::with_capacity_starts_empty ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_of_slice_u8 ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_of_slice_zst ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_zero ... ok
[INFO] [stdout] test counter::unit_tests::chars_count_new ... ok
[INFO] [stdout] test counter::unit_tests::chars_count_of_str_ascii ... ok
[INFO] [stdout] test counter::unit_tests::chars_count_of_str_emoji ... ok
[INFO] [stdout] test counter::unit_tests::chars_count_of_str_unicode ... ok
[INFO] [stdout] test counter::unit_tests::counter_kind_eq ... ok
[INFO] [stdout] test counter::unit_tests::counter_trait_dynamic_dispatch ... ok
[INFO] [stdout] test counter::collection::unit_tests::new_is_empty ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_of_str ... ok
[INFO] [stdout] test counter::collection::unit_tests::push_increments_len ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_new ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_of_slice_u32 ... ok
[INFO] [stdout] test counter::unit_tests::bytes_count_of_str_multibyte ... ok
[INFO] [stdout] test config::unit_tests::overwrite_threads_child_wins ... ok
[INFO] [stdout] test counter::unit_tests::items_count_new ... ok
[INFO] [stdout] test counter::unit_tests::items_count_of_empty_iter ... ok
[INFO] [stdout] test counter::unit_tests::cycles_count_new ... ok
[INFO] [stdout] test counter::unit_tests::items_count_of_iter ... ok
[INFO] [stdout] test entry::list::unit_tests::entry_list_push_and_iter ... ok
[INFO] [stdout] test counter::unit_tests::items_count_of_iter_consumes ... ok
[INFO] [stdout] test entry::tree::unit_tests::entry_tree_group_options ... ok
[INFO] [stdout] test entry::tree::unit_tests::sort_by_stats_missing_entries_sort_last ... ok
[INFO] [stdout] test entry::tree::unit_tests::entry_tree_grouping ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_values_threaded_four_threads ... ok
[INFO] [stdout] test entry::tree::unit_tests::natural_cmp_ordering ... ok
[INFO] [stdout] test output::csv::unit_tests::csv_output_header_and_row ... ok
[INFO] [stdout] test entry::tree::unit_tests::entry_tree_retain ... ok
[INFO] [stdout] test entry::tree::unit_tests::sort_by_stats_p50 ... ok
[INFO] [stdout] test output::csv::unit_tests::csv_multiple_rows ... ok
[INFO] [stdout] test entry::tree::unit_tests::sort_by_stats_name_delegates_to_sort ... ok
[INFO] [stdout] test output::csv::unit_tests::csv_empty_results ... ok
[INFO] [stdout] test output::csv::unit_tests::csv_threads_column_header_present ... ok
[INFO] [stdout] test output::csv::unit_tests::csv_threads_column_values ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_infinity_passthrough ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_bytes_binary ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_bytes_decimal ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_negative_sub_one ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_preserves_significant_digits ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_nan_passthrough ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_sub_one ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_negative ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_sub_one_with_leading_zeros ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_neg_infinity_passthrough ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_trims_trailing_zeros ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_format_throughput ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_value_binary_thresholds ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_value_ranges ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_truncates_not_rounds ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_value_nan ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_value_zero ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_whole_number ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_value_negative ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_bytes ... ok
[INFO] [stdout] test output::fmt::unit_tests::scale_format_bytes_format ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_bytes_binary_exact ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_bytes_decimal_exact ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_cycles ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_width_padding ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_zero_count ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_zero_picos ... ok
[INFO] [stdout] test output::fmt::unit_tests::throughput_display_items ... ok
[INFO] [stdout] test output::table::unit_tests::table_renders_header ... ok
[INFO] [stdout] test output::table::unit_tests::table_renders_row ... ok
[INFO] [stdout] test output::table::unit_tests::write_comparison_row_no_panic ... ok
[INFO] [stdout] test output::table::unit_tests::ignored_leaf_placeholder ... ok
[INFO] [stdout] test output::table::unit_tests::table_tree_structure ... ok
[INFO] [stdout] test stats::exact::unit_tests::compute_all_percentiles ... ok
[INFO] [stdout] test output::table::unit_tests::nested_group_tree_structure ... ok
[INFO] [stdout] test output::table::unit_tests::write_leaf_with_throughput ... ok
[INFO] [stdout] test stats::exact::unit_tests::mean_basic ... ok
[INFO] [stdout] test output::table::unit_tests::prefix_restores_after_nested_groups ... ok
[INFO] [stdout] test stats::exact::unit_tests::mean_single ... ok
[INFO] [stdout] test stats::exact::unit_tests::percentile_hundred_samples ... ok
[INFO] [stdout] test stats::exact::unit_tests::percentile_empty_panics - should panic ... ok
[INFO] [stdout] test stats::exact::unit_tests::std_dev_uniform ... ok
[INFO] [stdout] test stats::exact::unit_tests::percentile_out_of_range_panics - should panic ... ok
[INFO] [stdout] test stats::exact::unit_tests::percentile_single_sample ... ok
[INFO] [stdout] test stats::exact::unit_tests::percentile_two_samples ... ok
[INFO] [stdout] test stats::exact::unit_tests::mean_empty_panics - should panic ... ok
[INFO] [stdout] test stats::exact::unit_tests::std_dev_empty_panics - should panic ... ok
[INFO] [stdout] test stats::hdr::unit_tests::hdr_empty ... ok
[INFO] [stdout] test stats::sample::unit_tests::collection_add_and_sort ... ok
[INFO] [stdout] test output::fmt::unit_tests::format_f64_sub_one_two_sig_figs ... ok
[INFO] [stdout] test stats::sample::unit_tests::collection_new_is_empty ... ok
[INFO] [stdout] test stats::sample::unit_tests::collection_raw_picos_preserves_order ... ok
[INFO] [stdout] test stats::sample::unit_tests::collection_total_duration ... ok
[INFO] [stdout] test stats::sample::unit_tests::collection_total_iterations ... ok
[INFO] [stdout] test stats::sample::unit_tests::collection_with_capacity ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_exact_mode ... ok
[INFO] [stdout] test stats::hdr::unit_tests::hdr_basic_percentiles ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_exact_mode_unsorted_input ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_empty_panics - should panic ... ok
[INFO] [stdout] test stats::hdr::unit_tests::hdr_clamps_u128_to_u64 ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_exact_mode_with_sample_size ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_values_threaded_propagates_panic - should panic ... ok
[INFO] [stdout] test stats::unit_tests::exact_percentiles_match_uniform_analytical ... ok
[INFO] [stdout] test stats::exact::unit_tests::percentile_ten_samples ... ok
[INFO] [stdout] test stats::hdr::unit_tests::hdr_min_max_len ... ok
[INFO] [stdout] test stats::hdr::unit_tests::hdr_mean_and_stddev ... ok
[INFO] [stdout] test stats::hdr::unit_tests::hdr_single_value ... ok
[INFO] [stdout] test stats::exact::unit_tests::std_dev_identical_values ... ok
[INFO] [stdout] test cli::unit_tests::parse_threads_invalid ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_zero_sample_size_panics - should panic ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_counter_uses_constant_value ... ok
[INFO] [stdout] test stats::unit_tests::sample_sufficiency_config_too_low ... ok
[INFO] [stdout] test stats::unit_tests::hdr_wrapper_matches_raw_hdrhistogram ... ok
[INFO] [stdout] test stats::unit_tests::sample_sufficiency_very_low ... ok
[INFO] [stdout] test stats::unit_tests::cross_validate_exact_vs_hdr ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_threaded_generator_call_count ... ok
[INFO] [stdout] test thread::unit_tests::atomic_flag_roundtrip ... ok
[INFO] [stdout] test stats::unit_tests::sample_sufficiency_max_time_truncated ... ok
[INFO] [stdout] test thread::unit_tests::atomic_flag_default_false ... ok
[INFO] [stdout] test thread::unit_tests::atomic_flag_default_true ... ok
[INFO] [stdout] test thread::unit_tests::cache_padded_size ... ok
[INFO] [stdout] test thread::unit_tests::par_extend_one_aux ... ok
[INFO] [stdout] test thread::unit_tests::cache_padded_deref ... ok
[INFO] [stdout] test thread::unit_tests::cache_padded_deref_mut ... ok
[INFO] [stdout] test thread::unit_tests::par_extend_four_aux ... ok
[INFO] [stdout] test thread::unit_tests::par_extend_panic_leaves_none_slot ... ok
[INFO] [stdout] test thread::unit_tests::cache_padded_alignment ... ok
[INFO] [stdout] test thread::unit_tests::par_extend_zero_aux ... ok
[INFO] [stdout] test thread::unit_tests::broadcast_swallows_main_thread_panic ... ok
[INFO] [stdout] test thread::unit_tests::sync_wrap_deref ... ok
[INFO] [stdout] test thread::unit_tests::broadcast_swallows_aux_thread_panic ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::arithmetic_add ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::arithmetic_div_u64 ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::arithmetic_sub ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::checked_sub_none ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::checked_sub_some ... ok
[INFO] [stdout] test thread::unit_tests::sync_wrap_is_sync ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::display_milliseconds ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::add_assign ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::display_nanoseconds ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::display_microseconds ... ok
[INFO] [stdout] test thread::unit_tests::broadcast_thread_id_zero_is_main ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::display_seconds ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::from_duration_millis ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::from_duration_micros ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::display_picoseconds ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::from_duration_nanos ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::zero ... ok
[INFO] [stdout] test stats::unit_tests::sample_sufficiency_all_ok ... ok
[INFO] [stdout] test thread::unit_tests::pool_spawns_lazily ... ok
[INFO] [stdout] test thread::unit_tests::par_extend_scaling ... ok
[INFO] [stdout] test util::sort::unit_tests::natural_sort_order ... ok
[INFO] [stdout] test time::unit_tests::timer_overhead_nonnegative ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::ordering ... ok
[INFO] [stdout] test util::sort::unit_tests::natural_sort_mixed ... ok
[INFO] [stdout] test thread::unit_tests::broadcast_with_sleep ... ok
[INFO] [stdout] test time::unit_tests::measure_precision_nonzero ... ok
[INFO] [stdout] test time::unit_tests::timer_best_available_works ... ok
[INFO] [stdout] test time::unit_tests::timer_precision_nonzero ... ok
[INFO] [stdout] test time::unit_tests::instant_timer_measures_time ... ok
[INFO] [stdout] test time::fine_duration::unit_tests::arithmetic_mul_u64 ... ok
[INFO] [stdout] test thread::unit_tests::sync_wrap_deref_mut ... ok
[INFO] [stdout] test cli::unit_tests::parse_defaults ... ok
[INFO] [stdout] test bencher::unit_tests::with_inputs_bench_refs_threaded ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_hdr_mode ... ok
[INFO] [stdout] test bencher::unit_tests::counter_length_matches_actual_sample_count ... ok
[INFO] [stdout] test stats::unit_tests::compute_stats_hdr_boundary ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 241 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compile_fail.rs (/opt/rustwide/target/debug/deps/compile_fail-e8d01471796fb0d0)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]     Checking cfg-if v1.0.4
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]     Checking simd-adler32 v0.3.8
[INFO] [stderr]     Checking adler2 v2.0.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]     Checking minimal-lexical v0.2.1
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]     Checking memchr v2.8.0
[INFO] [stderr]     Checking byteorder v1.5.0
[INFO] [stderr]     Checking base64 v0.21.7
[INFO] [stderr]     Checking miniz_oxide v0.8.9
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]     Checking bitflags v2.11.0
[INFO] [stderr]     Checking scopeguard v1.2.0
[INFO] [stderr]     Checking smallvec v1.15.1
[INFO] [stderr]     Checking once_cell v1.21.3
[INFO] [stderr]     Checking linux-raw-sys v0.12.1
[INFO] [stderr]     Checking lock_api v0.4.14
[INFO] [stderr]     Checking hashbrown v0.14.5
[INFO] [stderr]     Checking rustc-hash v2.1.1
[INFO] [stderr]     Checking sdd v4.6.2
[INFO] [stderr]     Checking fastrand v2.3.0
[INFO] [stderr]     Checking flate2 v1.1.9
[INFO] [stderr]     Checking static_assertions v1.1.0
[INFO] [stderr]     Checking arrayvec v0.7.6
[INFO] [stderr]     Checking saa v5.5.0
[INFO] [stderr]     Checking crossbeam-channel v0.5.15
[INFO] [stderr]     Checking crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]     Checking scc v3.6.5
[INFO] [stderr]     Checking nom v7.1.3
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]     Checking hdrhistogram v7.5.4
[INFO] [stderr]     Checking seize v0.5.1
[INFO] [stderr]    Compiling libmimalloc-sys v0.1.44
[INFO] [stderr]     Checking tempfile v3.26.0
[INFO] [stderr]     Checking dashmap v6.1.0
[INFO] [stderr]     Checking mimalloc v0.1.48
[INFO] [stderr]     Checking masstree v0.8.1
[INFO] [stderr]    Compiling pbench-macros v0.2.0
[INFO] [stderr]     Checking pbench v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unnecessary `unsafe` block
[INFO] [stderr]   --> /opt/rustwide/workdir/src/time/tsc.rs:97:9
[INFO] [stderr]    |
[INFO] [stderr] 97 |         unsafe { x86::__cpuid(leaf) }
[INFO] [stderr]    |         ^^^^^^ unnecessary `unsafe` block
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `pbench` (lib) generated 1 warning
[INFO] [stderr]     Checking pbench-tests v0.0.0 (/opt/rustwide/target/tests/trybuild/pbench)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.03s
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stderr] test tests/compile_fail/duplicate_option.rs ... ok
[INFO] [stderr] test tests/compile_fail/invalid_args.rs ... ok
[INFO] [stderr] test tests/compile_fail/unknown_option.rs ... ok
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stdout] test compile_fail ... ok
[INFO] [stderr]      Running tests/integration.rs (/opt/rustwide/target/debug/deps/integration-791cf5045d3657d1)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 18.88s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pbench
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test src/bencher/mod.rs - bencher::Bencher<'ctx>::counter (line 172) ... ignored
[INFO] [stdout] test src/counter/mod.rs - counter::BytesCount (line 66) ... ignored
[INFO] [stdout] test src/lib.rs - (line 18) ... ignored
[INFO] [stdout] test src/lib.rs - (line 47) ... ignored
[INFO] [stdout] test src/lib.rs - (line 59) ... ignored
[INFO] [stdout] test src/lib.rs - (line 70) ... ignored
[INFO] [stdout] test src/lib.rs - (line 82) ... ignored
[INFO] [stdout] test src/config.rs - config::BenchOptions (line 20) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 7 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.44s; merged doctests compilation took 0.43s
[INFO] running `Command { std: "docker" "inspect" "d8963d2d6ad7d3d71eec193422852bfa7498fe074e2ea1b4a91eeed797cc6371", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d8963d2d6ad7d3d71eec193422852bfa7498fe074e2ea1b4a91eeed797cc6371", kill_on_drop: false }`
[INFO] [stdout] d8963d2d6ad7d3d71eec193422852bfa7498fe074e2ea1b4a91eeed797cc6371
